← Index
NYTProf Performance Profile   « line view »
For starman worker -M FindBin --max-requests 50 --workers 2 --user=kohadev-koha --group kohadev-koha --pid /var/run/koha/kohadev/plack.pid --daemonize --access-log /var/log/koha/kohadev/plack.log --error-log /var/log/koha/kohadev/plack-error.log -E deployment --socket /var/run/koha/kohadev/plack.sock /etc/koha/sites/kohadev/plack.psgi
  Run on Fri Jan 8 14:16:49 2016
Reported on Fri Jan 8 14:23:06 2016

Filename(eval 161)[/usr/share/perl5/Text/MicroTemplate.pm:389]
StatementsExecuted 0 statements in 0s
Subroutines
Calls P F Exclusive
Time
Inclusive
Time
Subroutine
21021020957.2ms215msbase::::import base::import (recurses: max depth 3, inclusive time 142ms)
45638327.7ms27.7msSub::Name::::subname Sub::Name::subname (xsub)
5201118.8ms19.7msFile::Spec::Unix::::abs2rel File::Spec::Unix::abs2rel
31116.9ms43.0msFile::Find::::find File::Find::find
11115.3ms36.7msDBI::::connect DBI::connect
245421814.4ms14.4msUNIVERSAL::::can UNIVERSAL::can (xsub)
3723311.4ms11.4msmro::::get_linear_isa mro::get_linear_isa (xsub)
1191111.3ms11.3msXML::SAX::Expat::::_handle_end XML::SAX::Expat::_handle_end
118124424010.2ms10.2msstrict::::import strict::import
117824123710.1ms10.1mswarnings::::import warnings::import
645669.04ms9.04msnext::::method next::method
530757.80ms203msTry::Tiny::::try Try::Tiny::try
5227277.40ms9.09msB::Hooks::EndOfScope::XS::::__ANON__ B::Hooks::EndOfScope::XS::__ANON__
3116.05ms2.29sKoha::Objects::::search Koha::Objects::search
95529185.46ms5.46msstrict::::unimport strict::unimport
9696473.46ms3.46msExporter::::import Exporter::import
119113.33ms3.33msXML::SAX::Expat::::_handle_start XML::SAX::Expat::_handle_start
4333.24ms3.39msConfig::::FETCH Config::FETCH
2626263.04ms3.71msnamespace::clean::::import namespace::clean::import
3112.68ms2.79msPlack::Sandbox::_2fetc_2fkoha_2fsites_2fkohadev_2fplack_2epsgi::::__ANON__Plack::Sandbox::_2fetc_2fkoha_2fsites_2fkohadev_2fplack_2epsgi::__ANON__
31641482.37ms2.37msScalar::Util::::weaken Scalar::Util::weaken (xsub)
382112.06ms2.06msXML::SAX::Expat::::_handle_char XML::SAX::Expat::_handle_char
1425812.00ms2.29msPackage::Stash::XS::::namespace Package::Stash::XS::namespace (xsub)
1111.47ms1.47msDynaLoader::::bootstrap DynaLoader::bootstrap
555581.29ms1.29msconstant::::import constant::import
170331.08ms1.08msList::Util::::first List::Util::first (xsub)
2221.05ms1.05msXSLoader::::load XSLoader::load
174174174988µs988µsutf8::::import utf8::import
332985µs985µsCGI::::AUTOLOAD CGI::AUTOLOAD
89152959µs959µsFile::Spec::Unix::::canonpath File::Spec::Unix::canonpath (xsub)
221952µs1.89msModule::Runtime::::require_module Module::Runtime::require_module
35354673µs673µsTry::Tiny::::catch Try::Tiny::catch
51711606µs606µsFile::Spec::Unix::::splitdir File::Spec::Unix::splitdir
53533572µs572µsScalar::Util::::blessed Scalar::Util::blessed (xsub)
72243558µs558µsScalar::Util::::reftype Scalar::Util::reftype (xsub)
333326514µs514µswarnings::::unimport warnings::unimport
52011370µs370µsFile::Spec::Unix::::curdir File::Spec::Unix::curdir
922333µs333µsCGI::Util::::rearrange CGI::Util::rearrange
665307µs307µsvars::::import vars::import
10241290µs290µsPackage::Stash::XS::::name Package::Stash::XS::name (xsub)
311195µs195µsFile::pushd::::pushd File::pushd::pushd
111174µs174µsDBI::db::::do DBI::db::do (xsub)
111171µs171µsClass::Accessor::::mk_accessors Class::Accessor::mk_accessors
311160µs160µsPlack::Component::::to_app_auto Plack::Component::to_app_auto
311155µs155µsCGI::::initialize_globals CGI::initialize_globals
444139µs139µsoverload::::import overload::import
6554139µs139µsUNIVERSAL::::isa UNIVERSAL::isa (xsub)
111135µs135µsSub::Exporter::Progressive::::import Sub::Exporter::Progressive::import
1453134µs134µsversion::vxs::::_VERSION version::vxs::_VERSION (xsub)
111126µs126µsModern::Perl::::import Modern::Perl::import
551106µs106µsDBD::_::common::::install_method DBD::_::common::install_method
31198µs98µsFile::pushd::::DESTROY File::pushd::DESTROY
77781µs81µsList::Util::::import List::Util::import
161178µs78µsXML::SAX::Expat::::_handle_comment XML::SAX::Expat::_handle_comment
33378µs78µsModule::Runtime::::import Module::Runtime::import
22277µs77µsCGI::::import CGI::import
262173µs86µsFile::Spec::Unix::::catdir File::Spec::Unix::catdir (xsub)
117462µs62µsDBI::common::::STORE DBI::common::STORE (xsub)
21149µs49µsIO::Handle::::read IO::Handle::read
42243µs43µsSelectSaver::::DESTROY SelectSaver::DESTROY
33341µs41µsConfig::::import Config::import
32141µs41µsModule::Runtime::::module_notional_filename Module::Runtime::module_notional_filename
11140µs40µsDBI::::_new_drh DBI::_new_drh
11137µs37µsModule::Runtime::::use_package_optimistically Module::Runtime::use_package_optimistically
54236µs36µsDBI::common::::FETCH DBI::common::FETCH (xsub)
11133µs33µsXML::Parser::Expat::::DESTROY XML::Parser::Expat::DESTROY
154432µs32µsCGI::::self_or_default CGI::self_or_default
61132µs32µsCGI::::param CGI::param
55528µs28µsmro::::import mro::import
22224µs24µsSub::Exporter::Progressive::::__ANON__ Sub::Exporter::Progressive::__ANON__
22224µs24µsModule::Runtime::::use_module Module::Runtime::use_module
11124µs24µsDBI::::_new_dbh DBI::_new_dbh
11116µs16µsC4::Context::::config C4::Context::config
52213µs13µsmro::::set_mro mro::set_mro (xsub)
31113µs13µsCGI::::charset CGI::charset
22212µs12µsC4::Context::::import C4::Context::import
1119µs9µsbytes::::import bytes::import
3119µs9µsoverload::::AddrRef overload::AddrRef
1117µs7µsClass::Accessor::::import Class::Accessor::import
1111µs1µsScalar::Util::::refaddr Scalar::Util::refaddr (xsub)
1111µs1µsInternals::::SvREADONLY Internals::SvREADONLY (xsub)
0000s0sPlack::Component::::__ANON__[:3] Plack::Component::__ANON__[:3]
0000s0sPlack::Component::::__ANON__[:72] Plack::Component::__ANON__[:72]
0000s0sPlack::Component::::__ANON__[:74] Plack::Component::__ANON__[:74]
Call graph for these subroutines as a Graphviz dot language file.
Line State
ments
Time
on line
Calls Time
in subs
Code
1package Plack::Component;
2sub {
3 local $SIG{__WARN__} = sub { print STDERR $_mt->_error(shift, 4, $_from) };
4 Text::MicroTemplate::encoded_string((
5 sub { my $_MT = ''; local $Plack::Component::_MTREF = \$_MT; my $_MT_T = '';my $stash = $_[0];
6;
7
- -
11$_MT .="\<script\ type\=\"text\/javascript\"\ charset\=\"utf\-8\"\>\n\ \ \ \ \/\/\ When\ jQuery\ is\ sourced\,\ it\'s\ going\ to\ overwrite\ whatever\ might\ be\ in\ the\n\ \ \ \ \/\/\ \'\$\'\ variable\,\ so\ store\ a\ reference\ of\ it\ in\ a\ temporary\ variable\.\.\.\n\ \ \ \ var\ _\$\ \=\ window\.\$\;\n\ \ \ \ if\ \(typeof\ jQuery\ \=\=\ \'undefined\'\)\ \{\n\ \ \ \ \ \ \ \ var\ jquery_url\ \=\ \'";$_MT_T = $stash->{BASE_URL} ;$_MT .= ref $_MT_T eq 'Text::MicroTemplate::EncodedString' ? $$_MT_T : do{ $_MT_T =~ s/([&><"'])/$Text::MicroTemplate::_escape_table{$1}/ge; $_MT_T; } ; $_MT_T = '';
12
- -
15$_MT .="\/debug_toolbar\/jquery\.js\'\;\n\ \ \ \ \ \ \ \ document\.write\(unescape\(\'\%3Cscript\ src\=\"\'\ \+\ jquery_url\ \+\ \'\"\ type\=\"text\/javascript\"\%3E\%3C\/script\%3E\'\)\)\;\n\ \ \ \ \}\n\<\/script\>\n\<script\ type\=\"text\/javascript\"\ src\=\"";$_MT_T = $stash->{BASE_URL} ;$_MT .= ref $_MT_T eq 'Text::MicroTemplate::EncodedString' ? $$_MT_T : do{ $_MT_T =~ s/([&><"'])/$Text::MicroTemplate::_escape_table{$1}/ge; $_MT_T; } ; $_MT_T = '';
16
- -
21$_MT .="\/debug_toolbar\/toolbar\.min\.js\"\>\<\/script\>\n\<script\ type\=\"text\/javascript\"\ charset\=\"utf\-8\"\>\n\ \ \ \ \/\/\ Now\ that\ jQuery\ is\ done\ loading\,\ put\ the\ \'\$\'\ variable\ back\ to\ what\ it\ was\.\.\.\n\ \ \ \ var\ \$\ \=\ _\$\;\n\<\/script\>\n\<style\ type\=\"text\/css\"\>\n\ \ \ \ \@import\ url\(";$_MT_T = $stash->{BASE_URL} ;$_MT .= ref $_MT_T eq 'Text::MicroTemplate::EncodedString' ? $$_MT_T : do{ $_MT_T =~ s/([&><"'])/$Text::MicroTemplate::_escape_table{$1}/ge; $_MT_T; } ; $_MT_T = '';
22
- -
25$_MT .="\/debug_toolbar\/toolbar\.min\.css\)\;\n\<\/style\>\n\<div\ id\=\"plDebug\"\>\n\ \ \ \ \<div\ style\=\"display\:none\;\"\ id\=\"plDebugToolbar\"\>\n\ \ \ \ \ \ \ \ \<ul\ id\=\"plDebugPanelList\"\>\n";
26if ($stash->{panels}) {
27;$_MT .="\ \ \ \ \ \ \ \ \ \ \ \ \<li\>\<a\ id\=\"plHideToolBarButton\"\ href\=\"\#\"\ title\=\"Hide\ Toolbar\"\>Hide\ \&raquo\;\<\/a\>\<\/li\>\n";
28} else {
29;$_MT .="\ \ \ \ \ \ \ \ \ \ \ \ \<li\ id\=\"plDebugButton\"\>DEBUG\<\/li\>\n";
30}
31for my $panel (reverse @{$stash->{panels}}) {
32;$_MT .="\ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \<li\>\n";
33if ($panel->content) {
34;$_MT .="\ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \<a\ href\=\"";$_MT_T = $panel->url ;$_MT .= ref $_MT_T eq 'Text::MicroTemplate::EncodedString' ? $$_MT_T : do{ $_MT_T =~ s/([&><"'])/$Text::MicroTemplate::_escape_table{$1}/ge; $_MT_T; } ; $_MT_T = '';$_MT .="\"\ title\=\"";$_MT_T = $panel->title ;$_MT .= ref $_MT_T eq 'Text::MicroTemplate::EncodedString' ? $$_MT_T : do{ $_MT_T =~ s/([&><"'])/$Text::MicroTemplate::_escape_table{$1}/ge; $_MT_T; } ; $_MT_T = '';$_MT .="\"\ class\=\"";$_MT_T = $panel->dom_id ;$_MT .= ref $_MT_T eq 'Text::MicroTemplate::EncodedString' ? $$_MT_T : do{ $_MT_T =~ s/([&><"'])/$Text::MicroTemplate::_escape_table{$1}/ge; $_MT_T; } ; $_MT_T = '';$_MT .="\"\>\n";
35} else {
36;$_MT .="\ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \<div\ class\=\"contentless\"\>\n";
37}
38;$_MT .="\ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ ";$_MT_T = $panel->nav_title ;$_MT .= ref $_MT_T eq 'Text::MicroTemplate::EncodedString' ? $$_MT_T : do{ $_MT_T =~ s/([&><"'])/$Text::MicroTemplate::_escape_table{$1}/ge; $_MT_T; } ; $_MT_T = '';$_MT .="\n";
39if ($panel->nav_subtitle) {
40;$_MT .="\ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \<br\>\<small\>";$_MT_T = $panel->nav_subtitle ;$_MT .= ref $_MT_T eq 'Text::MicroTemplate::EncodedString' ? $$_MT_T : do{ $_MT_T =~ s/([&><"'])/$Text::MicroTemplate::_escape_table{$1}/ge; $_MT_T; } ; $_MT_T = '';$_MT .="\<\/small\>\n";
41}
42if ($panel->content) {
43;$_MT .="\ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \<\/a\>\n";
44} else {
45;$_MT .="\ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \<\/div\>\n";
46}
47;$_MT .="\ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \<\/li\>\n";
48} # end for
49;
50
- -
53$_MT .="\ \ \ \ \ \ \ \ \<\/ul\>\n\ \ \ \ \<\/div\>\n\ \ \ \ \<div\ style\=\"display\:none\;\"\ id\=\"plDebugToolbarHandle\"\>\n\ \ \ \ \ \ \ \ \<a\ title\=\"Show\ Toolbar\"\ id\=\"plShowToolBarButton\"\ href\=\"\#\"\>\&laquo\;\<\/a\>\n\ \ \ \ \<\/div\>\n";
54for my $panel (reverse @{$stash->{panels}}) {
55if ($panel->content) {
56;$_MT .="\ \ \ \ \ \ \ \ \ \ \ \ \<div\ id\=\"";$_MT_T = $panel->dom_id ;$_MT .= ref $_MT_T eq 'Text::MicroTemplate::EncodedString' ? $$_MT_T : do{ $_MT_T =~ s/([&><"'])/$Text::MicroTemplate::_escape_table{$1}/ge; $_MT_T; } ; $_MT_T = '';
57
58
59$_MT .="\"\ class\=\"panelContent\"\>\n\ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \<div\ class\=\"plDebugPanelTitle\"\>\n\ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \<a\ href\=\"\"\ class\=\"plDebugClose\"\>Close\<\/a\>\n\ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \<h3\>";$_MT_T = $panel->title ;$_MT .= ref $_MT_T eq 'Text::MicroTemplate::EncodedString' ? $$_MT_T : do{ $_MT_T =~ s/([&><"'])/$Text::MicroTemplate::_escape_table{$1}/ge; $_MT_T; } ; $_MT_T = '';
60
61
62$_MT .="\<\/h3\>\n\ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \<\/div\>\n\ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \<div\ class\=\"plDebugPanelContent\"\>\n\ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \<div\ class\=\"scroll\"\>\n";
63my $content = ref $panel->content eq 'CODE' ? $panel->content->() : $panel->content;
64$content = Encode::encode('latin1', $content, Encode::FB_XMLCREF);
65;$_MT .="\ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ ";$_MT_T = Text::MicroTemplate::encoded_string($content) ;$_MT .= ref $_MT_T eq 'Text::MicroTemplate::EncodedString' ? $$_MT_T : do{ $_MT_T =~ s/([&><"'])/$Text::MicroTemplate::_escape_table{$1}/ge; $_MT_T; } ; $_MT_T = '';
66
67
68$_MT .="\n\ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \<\/div\>\n\ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \ \<\/div\>\n\ \ \ \ \ \ \ \ \ \ \ \ \<\/div\>\n";
69}
70} # end for
71;
72$_MT .="\ \ \ \ \<div\ id\=\"plDebugWindow\"\ class\=\"panelContent\"\>\<\/div\>\n\<\/div\>\n";return $_MT; }
73 )->(@_));
74}
75
76;
 
# spent 36µs within DBI::common::FETCH which was called 5 times, avg 7µs/call: # 2 times (11µs+0s) by DBIx::Class::Storage::DBI::_determine_driver at line 1255 of DBIx/Class/Storage/DBI.pm, avg 5µs/call # once (12µs+0s) by DBIx::Class::Storage::DBI::mysql::_run_connection_actions at line 94 of DBIx/Class/Storage/DBI/mysql.pm # once (6µs+0s) by Try::Tiny::try at line 1492 of DBIx/Class/Storage/DBI.pm # once (6µs+0s) by DBIx::Class::Storage::DBI::_connect at line 1531 of DBIx/Class/Storage/DBI.pm
sub DBI::common::FETCH; # xsub
# spent 62µs within DBI::common::STORE which was called 11 times, avg 6µs/call: # 3 times (9µs+0s) by DBI::connect at line 723 of DBI.pm, avg 3µs/call # 3 times (6µs+0s) by DBI::connect at line 726 of DBI.pm, avg 2µs/call # once (20µs+0s) by DBD::mysql::dr::connect at line 155 of DBD/mysql.pm # once (10µs+0s) by DBI::connect at line 742 of DBI.pm # once (10µs+0s) by Koha::Objects::search at line 91 of Koha/Database.pm # once (6µs+0s) by Koha::Objects::search at line 95 of Koha/Database.pm # once (2µs+0s) by DBIx::Class::Storage::DBI::mysql::_run_connection_actions at line 94 of DBIx/Class/Storage/DBI/mysql.pm
sub DBI::common::STORE; # xsub
# spent 174µs within DBI::db::do which was called: # once (174µs+0s) by DBIx::Class::Storage::DBI::__ANON__[/usr/share/perl5/DBIx/Class/Storage/DBI.pm:1440] at line 1438 of DBIx/Class/Storage/DBI.pm
sub DBI::db::do; # xsub
# spent 959µs within File::Spec::Unix::canonpath which was called 891 times, avg 1µs/call: # 517 times (652µs+0s) by File::Spec::Unix::abs2rel at line 266 of File/Spec/Unix.pm, avg 1µs/call # 174 times (151µs+0s) by File::Spec::Unix::abs2rel at line 225 of File/Spec/Unix.pm, avg 870ns/call # 174 times (143µs+0s) by File::Spec::Unix::abs2rel at line 226 of File/Spec/Unix.pm, avg 823ns/call # 24 times (11µs+0s) by File::Spec::Unix::catdir at line 190 of Module/Find.pm, avg 462ns/call # 2 times (2µs+0s) by File::Spec::Unix::catdir at line 183 of Module/Find.pm, avg 1µs/call
sub File::Spec::Unix::canonpath; # xsub
# spent 86µs (73+13) within File::Spec::Unix::catdir which was called 26 times, avg 3µs/call: # 24 times (54µs+11µs) by Module::Find::_find at line 190 of Module/Find.pm, avg 3µs/call # 2 times (18µs+2µs) by Module::Find::_find at line 183 of Module/Find.pm, avg 10µs/call
sub File::Spec::Unix::catdir; # xsub
# spent 1µs within Internals::SvREADONLY which was called: # once (1µs+0s) by Class::C3::Componentised::ensure_class_loaded at line 1848 of DBIx/Class/ResultSource.pm
sub Internals::SvREADONLY; # xsub
# spent 1.08ms within List::Util::first which was called 170 times, avg 6µs/call: # 151 times (1.04ms+0s) by DBIx::Class::ResultSource::columns_info at line 472 of DBIx/Class/ResultSource.pm, avg 7µs/call # 16 times (35µs+0s) by DBIx::Class::Componentised::inject_base at line 203 of Class/C3/Componentised.pm, avg 2µs/call # 3 times (8µs+0s) by DBIx::Class::ResultSet::search_rs at line 467 of DBIx/Class/ResultSet.pm, avg 3µs/call
sub List::Util::first; # xsub
# spent 290µs within Package::Stash::XS::name which was called 102 times, avg 3µs/call: # 26 times (30µs+0s) by Package::Stash::XS::namespace at line 381 of namespace/clean.pm, avg 1µs/call # 26 times (13µs+0s) by Package::Stash::XS::namespace at line 363 of namespace/clean.pm, avg 488ns/call # 25 times (236µs+0s) by Package::Stash::XS::namespace at line 213 of namespace/clean.pm, avg 9µs/call # 25 times (11µs+0s) by Package::Stash::XS::namespace at line 308 of namespace/clean.pm, avg 448ns/call
sub Package::Stash::XS::name; # xsub
# spent 2.29ms (2.00+290µs) within Package::Stash::XS::namespace which was called 1425 times, avg 2µs/call: # 660 times (585µs+0s) by B::Hooks::EndOfScope::XS::__ANON__ at line 237 of namespace/clean.pm, avg 886ns/call # 191 times (262µs+30µs) by namespace::clean::import at line 381 of namespace/clean.pm, avg 2µs/call # 165 times (780µs+236µs) by B::Hooks::EndOfScope::XS::__ANON__ at line 213 of namespace/clean.pm, avg 6µs/call # 165 times (153µs+11µs) by namespace::clean::import at line 308 of namespace/clean.pm, avg 996ns/call # 165 times (96µs+0s) by B::Hooks::EndOfScope::XS::__ANON__ at line 241 of namespace/clean.pm, avg 579ns/call # 52 times (108µs+13µs) by namespace::clean::import at line 363 of namespace/clean.pm, avg 2µs/call # 26 times (14µs+0s) by namespace::clean::import at line 365 of namespace/clean.pm, avg 519ns/call # once (500ns+0s) by B::Hooks::EndOfScope::XS::__ANON__ at line 250 of namespace/clean.pm
sub Package::Stash::XS::namespace; # xsub
# spent 572µs within Scalar::Util::blessed which was called 535 times, avg 1µs/call: # 357 times (183µs+0s) by DBIx::Class::AccessorGroup::get_component_class at line 16 of DBIx/Class/AccessorGroup.pm, avg 513ns/call # 174 times (385µs+0s) by DBIx::Class::ResultSourceProxy::Table::table at line 84 of DBIx/Class/ResultSourceProxy/Table.pm, avg 2µs/call # 4 times (4µs+0s) by Method::Generate::Accessor::_generate_call_code at line 459 of Method/Generate/Accessor.pm, avg 925ns/call
sub Scalar::Util::blessed; # xsub
# spent 1µs within Scalar::Util::refaddr which was called: # once (1µs+0s) by DBIx::Class::Storage::DBI::_arm_global_destructor at line 221 of DBIx/Class/Storage/DBI.pm
sub Scalar::Util::refaddr; # xsub
# spent 558µs within Scalar::Util::reftype which was called 722 times, avg 773ns/call: # 540 times (430µs+0s) by Class::Accessor::Grouped::get_inherited at line 364 of Class/Accessor/Grouped.pm, avg 797ns/call # 180 times (124µs+0s) by Class::Accessor::Grouped::set_inherited at line 410 of Class/Accessor/Grouped.pm, avg 689ns/call # once (3µs+0s) by DBIx::Class::Storage::BlockRunner::run at line 112 of DBIx/Class/Storage/BlockRunner.pm # once (1µs+0s) by DBIx::Class::Storage::BlockRunner::new at line 82 of (eval 1105)[Sub/Quote.pm:5]
sub Scalar::Util::reftype; # xsub
# spent 2.37ms within Scalar::Util::weaken which was called 3164 times, avg 749ns/call: # 541 times (568µs+0s) by Sub::Defer::defer_sub at line 59 of Sub/Defer.pm, avg 1µs/call # 541 times (266µs+0s) by Sub::Defer::defer_sub at line 60 of Sub/Defer.pm, avg 491ns/call # 539 times (512µs+0s) by Sub::Quote::quote_sub at line 102 of Sub/Quote.pm, avg 950ns/call # 539 times (284µs+0s) by Sub::Quote::quote_sub at line 103 of Sub/Quote.pm, avg 527ns/call # 539 times (250µs+0s) by Sub::Quote::quote_sub at line 104 of Sub/Quote.pm, avg 464ns/call # 175 times (184µs+0s) by DBIx::Class::AccessorGroup::get_component_class at line 25 of DBIx/Class/AccessorGroup.pm, avg 1µs/call # 174 times (174µs+0s) by DBIx::Class::Schema::_register_source at line 1357 of DBIx/Class/Schema.pm, avg 998ns/call # 78 times (70µs+0s) by Class::Accessor::Grouped::__ANON__[/usr/share/perl5/Class/Accessor/Grouped.pm:942] at line 916 of Class/Accessor/Grouped.pm, avg 899ns/call # 24 times (34µs+0s) by DBIx::Class::ResultSet::_result_class or DBIx::Class::ResultSet::result_source or DBIx::Class::ResultSource::_columns or DBIx::Class::ResultSource::_ordered_columns or DBIx::Class::ResultSource::_primaries or DBIx::Class::ResultSource::_relationships or DBIx::Class::ResultSource::_unique_constraints or DBIx::Class::ResultSource::name or DBIx::Class::ResultSource::source_name or DBIx::Class::Storage::DBI::_conn_pid or DBIx::Class::Storage::DBI::_connect_info or DBIx::Class::Storage::DBI::_dbh or DBIx::Class::Storage::DBI::_dbh_autocommit or DBIx::Class::Storage::DBI::_dbh_details or DBIx::Class::Storage::DBI::_dbic_connect_attributes or DBIx::Class::Storage::DBI::_driver_determined or DBIx::Class::Storage::DBI::_sql_maker or DBIx::Class::Storage::DBI::_sql_maker_opts or DBIx::Class::Storage::DBI::on_connect_call or DBIx::Class::Storage::DBI::on_connect_do or DBIx::Class::Storage::DBI::unsafe or DBIx::Class::Storage::debug or DBIx::Class::Storage::schema or DBIx::Class::Storage::transaction_depth at line 906 of Class/Accessor/Grouped.pm, avg 1µs/call # 10 times (20µs+0s) by Sub::Quote::unquote_sub at line 163 of Sub/Quote.pm, avg 2µs/call # once (2µs+0s) by DBIx::Class::Storage::BlockRunner::_run at line 132 of DBIx/Class/Storage/BlockRunner.pm # once (2µs+0s) by DBIx::Class::Storage::BlockRunner::_run at line 133 of DBIx/Class/Storage/BlockRunner.pm # once (1µs+0s) by DBIx::Class::Storage::set_schema at line 75 of DBIx/Class/Storage.pm # once (1µs+0s) by DBIx::Class::Storage::DBI::_arm_global_destructor at line 221 of DBIx/Class/Storage/DBI.pm
sub Scalar::Util::weaken; # xsub
# spent 27.7ms within Sub::Name::subname which was called 4563 times, avg 6µs/call: # 3932 times (20.3ms+0s) by Class::Accessor::Grouped::_mk_group_accessors at line 151 of Class/Accessor/Grouped.pm, avg 5µs/call # 547 times (2.21ms+0s) by Moo::_Utils::_name_coderef at line 96 of Moo/_Utils.pm, avg 4µs/call # 24 times (111µs+0s) by DBIx::Class::ResultSet::_result_class or DBIx::Class::ResultSet::result_source or DBIx::Class::ResultSource::_columns or DBIx::Class::ResultSource::_ordered_columns or DBIx::Class::ResultSource::_primaries or DBIx::Class::ResultSource::_relationships or DBIx::Class::ResultSource::_unique_constraints or DBIx::Class::ResultSource::name or DBIx::Class::ResultSource::source_name or DBIx::Class::Storage::DBI::_conn_pid or DBIx::Class::Storage::DBI::_connect_info or DBIx::Class::Storage::DBI::_dbh or DBIx::Class::Storage::DBI::_dbh_autocommit or DBIx::Class::Storage::DBI::_dbh_details or DBIx::Class::Storage::DBI::_dbic_connect_attributes or DBIx::Class::Storage::DBI::_driver_determined or DBIx::Class::Storage::DBI::_sql_maker or DBIx::Class::Storage::DBI::_sql_maker_opts or DBIx::Class::Storage::DBI::on_connect_call or DBIx::Class::Storage::DBI::on_connect_do or DBIx::Class::Storage::DBI::unsafe or DBIx::Class::Storage::debug or DBIx::Class::Storage::schema or DBIx::Class::Storage::transaction_depth at line 898 of Class/Accessor/Grouped.pm, avg 5µs/call # 12 times (4.77ms+0s) by DBIx::Class::Relationship::ManyToMany::many_to_many at line 109 of DBIx/Class/Relationship/ManyToMany.pm, avg 398µs/call # 12 times (141µs+0s) by DBIx::Class::Relationship::ManyToMany::many_to_many at line 127 of DBIx/Class/Relationship/ManyToMany.pm, avg 12µs/call # 12 times (58µs+0s) by DBIx::Class::Relationship::ManyToMany::many_to_many at line 70 of DBIx/Class/Relationship/ManyToMany.pm, avg 5µs/call # 12 times (48µs+0s) by DBIx::Class::Relationship::ManyToMany::many_to_many at line 78 of DBIx/Class/Relationship/ManyToMany.pm, avg 4µs/call # 12 times (47µs+0s) by DBIx::Class::Relationship::ManyToMany::many_to_many at line 146 of DBIx/Class/Relationship/ManyToMany.pm, avg 4µs/call
sub Sub::Name::subname; # xsub
# spent 14.4ms within UNIVERSAL::can which was called 2454 times, avg 6µs/call: # 1920 times (10.2ms+0s) by Class::Accessor::Grouped::_mk_group_accessors at line 91 of Class/Accessor/Grouped.pm, avg 5µs/call # 174 times (2.71ms+0s) by DBIx::Class::ResultSourceProxy::Table::table at line 91 of DBIx/Class/ResultSourceProxy/Table.pm, avg 16µs/call # 174 times (374µs+0s) by DBIx::Class::ResultSourceProxy::Table::table at line 99 of DBIx/Class/ResultSourceProxy/Table.pm, avg 2µs/call # 48 times (697µs+0s) by DBIx::Class::Relationship::ManyToMany::many_to_many at line 39 of DBIx/Class/Relationship/ManyToMany.pm, avg 15µs/call # 48 times (193µs+0s) by DBIx::Class::ResultSet::_result_class or DBIx::Class::ResultSet::result_source or DBIx::Class::ResultSource::_columns or DBIx::Class::ResultSource::_ordered_columns or DBIx::Class::ResultSource::_primaries or DBIx::Class::ResultSource::_relationships or DBIx::Class::ResultSource::_unique_constraints or DBIx::Class::ResultSource::name or DBIx::Class::ResultSource::source_name or DBIx::Class::Storage::DBI::_conn_pid or DBIx::Class::Storage::DBI::_connect_info or DBIx::Class::Storage::DBI::_dbh or DBIx::Class::Storage::DBI::_dbh_autocommit or DBIx::Class::Storage::DBI::_dbh_details or DBIx::Class::Storage::DBI::_dbic_connect_attributes or DBIx::Class::Storage::DBI::_driver_determined or DBIx::Class::Storage::DBI::_sql_maker or DBIx::Class::Storage::DBI::_sql_maker_opts or DBIx::Class::Storage::DBI::on_connect_call or DBIx::Class::Storage::DBI::on_connect_do or DBIx::Class::Storage::DBI::unsafe or DBIx::Class::Storage::debug or DBIx::Class::Storage::schema or DBIx::Class::Storage::transaction_depth at line 815 of Class/Accessor/Grouped.pm, avg 4µs/call # 24 times (49µs+0s) by DBIx::Class::ResultSet::_result_class or DBIx::Class::ResultSet::result_source or DBIx::Class::ResultSource::_columns or DBIx::Class::ResultSource::_ordered_columns or DBIx::Class::ResultSource::_primaries or DBIx::Class::ResultSource::_relationships or DBIx::Class::ResultSource::_unique_constraints or DBIx::Class::ResultSource::name or DBIx::Class::ResultSource::source_name or DBIx::Class::Storage::DBI::_conn_pid or DBIx::Class::Storage::DBI::_connect_info or DBIx::Class::Storage::DBI::_dbh or DBIx::Class::Storage::DBI::_dbh_autocommit or DBIx::Class::Storage::DBI::_dbh_details or DBIx::Class::Storage::DBI::_dbic_connect_attributes or DBIx::Class::Storage::DBI::_driver_determined or DBIx::Class::Storage::DBI::_sql_maker or DBIx::Class::Storage::DBI::_sql_maker_opts or DBIx::Class::Storage::DBI::on_connect_call or DBIx::Class::Storage::DBI::on_connect_do or DBIx::Class::Storage::DBI::unsafe or DBIx::Class::Storage::debug or DBIx::Class::Storage::schema or DBIx::Class::Storage::transaction_depth at line 837 of Class/Accessor/Grouped.pm, avg 2µs/call # 24 times (48µs+0s) by DBIx::Class::ResultSet::_result_class or DBIx::Class::ResultSet::result_source or DBIx::Class::ResultSource::_columns or DBIx::Class::ResultSource::_ordered_columns or DBIx::Class::ResultSource::_primaries or DBIx::Class::ResultSource::_relationships or DBIx::Class::ResultSource::_unique_constraints or DBIx::Class::ResultSource::name or DBIx::Class::ResultSource::source_name or DBIx::Class::Storage::DBI::_conn_pid or DBIx::Class::Storage::DBI::_connect_info or DBIx::Class::Storage::DBI::_dbh or DBIx::Class::Storage::DBI::_dbh_autocommit or DBIx::Class::Storage::DBI::_dbh_details or DBIx::Class::Storage::DBI::_dbic_connect_attributes or DBIx::Class::Storage::DBI::_driver_determined or DBIx::Class::Storage::DBI::_sql_maker or DBIx::Class::Storage::DBI::_sql_maker_opts or DBIx::Class::Storage::DBI::on_connect_call or DBIx::Class::Storage::DBI::on_connect_do or DBIx::Class::Storage::DBI::unsafe or DBIx::Class::Storage::debug or DBIx::Class::Storage::schema or DBIx::Class::Storage::transaction_depth at line 860 of Class/Accessor/Grouped.pm, avg 2µs/call # 18 times (46µs+0s) by Class::C3::Componentised::ensure_class_loaded at line 119 of DBIx/Class/Storage/DBI.pm, avg 3µs/call # 4 times (11µs+0s) by Method::Generate::Accessor::_generate_xs at line 646 of Method/Generate/Accessor.pm, avg 3µs/call # 2 times (15µs+0s) by Method::Generate::Constructor::generate_method at line 103 of Method/Generate/Constructor.pm, avg 7µs/call # 2 times (10µs+0s) by Method::Generate::Constructor::generate_method at line 94 of Method/Generate/Constructor.pm, avg 5µs/call # 2 times (8µs+0s) by Moo::_constructor_maker_for at line 155 of Moo.pm, avg 4µs/call # 2 times (6µs+0s) by Method::Generate::Constructor::generate_method at line 109 of Method/Generate/Constructor.pm, avg 3µs/call # 2 times (5µs+0s) by Method::Generate::Constructor::new or Moo::Object::new at line 13 of Moo/Object.pm, avg 3µs/call # 2 times (4µs+0s) by Method::Generate::Constructor::new or Moo::Object::new at line 22 of Moo/Object.pm, avg 2µs/call # 2 times (4µs+0s) by Moo::_constructor_maker_for at line 157 of Moo.pm, avg 2µs/call # 2 times (4µs+0s) by Moo::_accessor_maker_for at line 128 of Moo.pm, avg 2µs/call # once (7µs+0s) by DBIx::Class::Storage::DBI::_determine_driver at line 1288 of DBIx/Class/Storage/DBI.pm # once (7µs+0s) by Moo::__ANON__[/usr/share/perl5/Moo.pm:183] at line 179 of Moo.pm # once (3µs+0s) by base::import at line 780 of Class/Accessor/Grouped.pm # once (1µs+0s) by base::import at line 781 of Class/Accessor/Grouped.pm
sub UNIVERSAL::can; # xsub
# spent 139µs within UNIVERSAL::isa which was called 65 times, avg 2µs/call: # 32 times (52µs+0s) by DBIx::Class::Componentised::inject_base at line 38 of DBIx/Class/Componentised.pm, avg 2µs/call # 16 times (36µs+0s) by DBIx::Class::Componentised::inject_base at line 201 of Class/C3/Componentised.pm, avg 2µs/call # 8 times (20µs+0s) by DBIx::Class::Componentised::inject_base at line 20 of DBIx/Class/Componentised.pm, avg 2µs/call # 6 times (28µs+0s) by DBIx::Class::ResultSet::new at line 310 of DBIx/Class/ResultSet.pm, avg 5µs/call # 3 times (4µs+0s) by CGI::header at line 17 of (eval 1110)[CGI.pm:932], avg 1µs/call
sub UNIVERSAL::isa; # xsub
# spent 11.4ms within mro::get_linear_isa which was called 372 times, avg 31µs/call: # 182 times (522µs+0s) by Class::Accessor::Grouped::get_super_paths at line 507 of Class/Accessor/Grouped.pm, avg 3µs/call # 174 times (10.8ms+0s) by DBIx::Class::Schema::CORE:sort at line 244 of DBIx/Class/Schema.pm, avg 62µs/call # 16 times (24µs+0s) by DBIx::Class::Componentised::inject_base at line 203 of Class/C3/Componentised.pm, avg 2µs/call
sub mro::get_linear_isa; # xsub
# spent 13µs within mro::set_mro which was called 5 times, avg 3µs/call: # 4 times (9µs+0s) by DBIx::Class::Componentised::inject_base at line 194 of Class/C3/Componentised.pm, avg 2µs/call # once (4µs+0s) by DBIx::Class::Storage::DBI::_determine_driver at line 1265 of DBIx/Class/Storage/DBI.pm
sub mro::set_mro; # xsub
# spent 134µs within version::vxs::_VERSION which was called 14 times, avg 10µs/call: # 10 times (112µs+0s) by strictures::VERSION at line 22 of strictures.pm, avg 11µs/call # once (8µs+0s) by Class::Accessor::Grouped::BEGIN@31 at line 50 of Class/Accessor/Grouped.pm # once (7µs+0s) by Method::Generate::Accessor::BEGIN@11 at line 17 of Method/Generate/Accessor.pm # once (4µs+0s) by Class::Accessor::Grouped::BEGIN@31 at line 51 of Class/Accessor/Grouped.pm # once (4µs+0s) by Method::Generate::Accessor::BEGIN@11 at line 21 of Method/Generate/Accessor.pm
sub version::vxs::_VERSION; # xsub